[INFO] cloning repository https://github.com/hTuneSys/hexaTuneDsp
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/hTuneSys/hexaTuneDsp" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FhTuneSys%2FhexaTuneDsp", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FhTuneSys%2FhexaTuneDsp'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 601506987b2edf53c12f9a7cdfee6ffa2e809b3a
[INFO] testing hTuneSys/hexaTuneDsp against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FhTuneSys%2FhexaTuneDsp" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/hTuneSys/hexaTuneDsp
[INFO] finished tweaking git repo https://github.com/hTuneSys/hexaTuneDsp
[INFO] tweaked toml for git repo https://github.com/hTuneSys/hexaTuneDsp written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/hTuneSys/hexaTuneDsp on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/hTuneSys/hexaTuneDsp already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded cbindgen v0.29.2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 6b663d76f7ae8f14857fd7b773cfa49ee0e62d2b15a580fd418f8fe8dc634dfa
[INFO] running `Command { std: "docker" "start" "-a" "6b663d76f7ae8f14857fd7b773cfa49ee0e62d2b15a580fd418f8fe8dc634dfa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "6b663d76f7ae8f14857fd7b773cfa49ee0e62d2b15a580fd418f8fe8dc634dfa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6b663d76f7ae8f14857fd7b773cfa49ee0e62d2b15a580fd418f8fe8dc634dfa", kill_on_drop: false }`
[INFO] [stdout] 6b663d76f7ae8f14857fd7b773cfa49ee0e62d2b15a580fd418f8fe8dc634dfa
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 601f3ff63bdebb261281859fe3208346342f528f8f7e2f95e39b6ee71ba0c9ad
[INFO] running `Command { std: "docker" "start" "-a" "601f3ff63bdebb261281859fe3208346342f528f8f7e2f95e39b6ee71ba0c9ad", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling unicode-ident v1.0.24
[INFO] [stderr]    Compiling quote v1.0.45
[INFO] [stderr]    Compiling libc v0.2.182
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling getrandom v0.4.2
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling zmij v1.0.21
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling proc-macro2 v1.0.106
[INFO] [stderr]    Compiling anstyle v1.0.13
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling rustix v1.1.4
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling bitflags v2.11.0
[INFO] [stderr]    Compiling winnow v0.7.15
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling linux-raw-sys v0.12.1
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling clap_lex v1.0.0
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling clap_builder v4.5.60
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling cbindgen v0.29.2
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling itoa v1.0.17
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling hound v3.5.1
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling tempfile v3.26.0
[INFO] [stderr]    Compiling toml_parser v1.0.9+spec-1.1.0
[INFO] [stderr]    Compiling serde_spanned v1.0.4
[INFO] [stderr]    Compiling toml_datetime v0.7.5+spec-1.1.0
[INFO] [stderr]    Compiling toml v0.9.12+spec-1.1.0
[INFO] [stderr]    Compiling clap v4.5.60
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling hexatune-dsp-ffi v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 40.95s
[INFO] running `Command { std: "docker" "inspect" "601f3ff63bdebb261281859fe3208346342f528f8f7e2f95e39b6ee71ba0c9ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "601f3ff63bdebb261281859fe3208346342f528f8f7e2f95e39b6ee71ba0c9ad", kill_on_drop: false }`
[INFO] [stdout] 601f3ff63bdebb261281859fe3208346342f528f8f7e2f95e39b6ee71ba0c9ad
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3de8ab6f652b0eb6d8fa5a6da59cdfe6779401ac1f6842b3faa925cb19312831
[INFO] running `Command { std: "docker" "start" "-a" "3de8ab6f652b0eb6d8fa5a6da59cdfe6779401ac1f6842b3faa925cb19312831", kill_on_drop: false }`
[INFO] [stderr]    Compiling hexatune-dsp-ffi v0.1.2 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.09s
[INFO] running `Command { std: "docker" "inspect" "3de8ab6f652b0eb6d8fa5a6da59cdfe6779401ac1f6842b3faa925cb19312831", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3de8ab6f652b0eb6d8fa5a6da59cdfe6779401ac1f6842b3faa925cb19312831", kill_on_drop: false }`
[INFO] [stdout] 3de8ab6f652b0eb6d8fa5a6da59cdfe6779401ac1f6842b3faa925cb19312831
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] cb7c6f259e9afb178052ec426872e75db5af46440ecdaec8e65c7c429e58b3be
[INFO] running `Command { std: "docker" "start" "-a" "cb7c6f259e9afb178052ec426872e75db5af46440ecdaec8e65c7c429e58b3be", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/hexatune_dsp_ffi-12f8b4f8a9214612)
[INFO] [stdout] 
[INFO] [stdout] running 60 tests
[INFO] [stdout] test binaural::tests::set_delta_changes_output ... ok
[INFO] [stdout] test binaural::tests::am_mode_produces_identical_channels ... ok
[INFO] [stdout] test binaural::tests::binaural_produces_different_channels ... ok
[INFO] [stdout] test engine::tests::clear_base_also_clears_textures_and_events ... ok
[INFO] [stdout] test engine::tests::engine_creates_successfully ... ok
[INFO] [stdout] test engine::tests::event_requires_base ... ok
[INFO] [stdout] test engine::tests::gain_updates_are_applied ... ok
[INFO] [stdout] test engine::tests::config_update_changes_behavior ... ok
[INFO] [stdout] test engine::tests::base_layer_contributes_to_output ... ok
[INFO] [stdout] test engine::tests::output_stays_in_range ... ok
[INFO] [stdout] test engine::tests::start_stop_transitions ... ok
[INFO] [stdout] test engine::tests::texture_index_bounds_checked ... ok
[INFO] [stdout] test engine::tests::renders_audio_when_running ... ok
[INFO] [stdout] test engine::tests::renders_silence_when_stopped ... ok
[INFO] [stdout] test engine::tests::texture_requires_base ... ok
[INFO] [stdout] test event_player::tests::clear_all_stops_playback ... ok
[INFO] [stdout] test event_player::tests::empty_system_returns_silence ... ok
[INFO] [stdout] test event_player::tests::event_plays_and_finishes ... ok
[INFO] [stdout] test event_player::tests::max_one_concurrent_event ... ok
[INFO] [stdout] test event_player::tests::pan_affects_stereo_output ... ok
[INFO] [stdout] test event_player::tests::set_and_clear_event ... ok
[INFO] [stdout] test event_scheduler::tests::scheduler_triggers_at_zero_countdown ... ok
[INFO] [stdout] test event_player::tests::stereo_event_loads_correctly ... ok
[INFO] [stdout] test event_scheduler::tests::xorshift64_f32_in_range ... ok
[INFO] [stdout] test event_scheduler::tests::scheduler_counts_down ... ok
[INFO] [stdout] test event_scheduler::tests::xorshift64_produces_different_values ... ok
[INFO] [stdout] test event_scheduler::tests::xorshift64_range_u64_respects_bounds ... ok
[INFO] [stdout] test event_scheduler::tests::zero_seed_becomes_one ... ok
[INFO] [stdout] test mixer::tests::default_gains_are_correct ... ok
[INFO] [stdout] test mixer::tests::mix_applies_gains ... ok
[INFO] [stdout] test mixer::tests::master_gain_scales_everything ... ok
[INFO] [stdout] test mixer::tests::mix_zero_gain_produces_silence ... ok
[INFO] [stdout] test mixer::tests::output_is_clamped ... ok
[INFO] [stdout] test event_player::tests::rejects_invalid_index ... ok
[INFO] [stdout] test oscillator::tests::oscillator_produces_sine_at_correct_frequency ... ok
[INFO] [stdout] test event_scheduler::tests::scheduler_disabled_returns_none ... ok
[INFO] [stdout] test sample_player::tests::empty_player_returns_silence ... ok
[INFO] [stdout] test sample_player::tests::load_raw_pcm_mono ... ok
[INFO] [stdout] test sample_player::tests::load_raw_pcm_stereo ... ok
[INFO] [stdout] test event_scheduler::tests::scheduler_round_robins_slots ... ok
[INFO] [stdout] test oscillator::tests::set_frequency_preserves_phase ... ok
[INFO] [stdout] test sample_player::tests::mono_load_duplicates_channels ... ok
[INFO] [stdout] test mixer::tests::all_layers_contribute ... ok
[INFO] [stdout] test event_scheduler::tests::xorshift64_range_f32_respects_bounds ... ok
[INFO] [stdout] test sample_player::tests::crossfade_blends_at_loop_boundary ... ok
[INFO] [stdout] test sample_player::tests::crossfade_clamped_for_short_buffers ... ok
[INFO] [stdout] test sample_player::tests::loops_at_end_of_buffer ... ok
[INFO] [stdout] test sample_player::tests::stereo_load_deinterleaves ... ok
[INFO] [stdout] test scheduler::tests::graceful_stop_at_cycle_end ... ok
[INFO] [stdout] test oscillator::tests::output_stays_in_range ... ok
[INFO] [stdout] test scheduler::tests::oneshot_plays_in_first_iteration ... ok
[INFO] [stdout] test scheduler::tests::set_items_resets_state ... ok
[INFO] [stdout] test scheduler::tests::cycle_count_increments ... ok
[INFO] [stdout] test scheduler::tests::cycles_through_items ... ok
[INFO] [stdout] test scheduler::tests::empty_schedule_returns_no_change ... ok
[INFO] [stdout] test scheduler::tests::graceful_stop_with_oneshot ... ok
[INFO] [stdout] test scheduler::tests::oneshot_skipped_in_second_iteration ... ok
[INFO] [stdout] test scheduler::tests::all_oneshot_exhausts_after_first_cycle ... ok
[INFO] [stdout] test scheduler::tests::reset_clears_all_state ... ok
[INFO] [stdout] test scheduler::tests::single_item_stays_forever ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 60 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests hexatune_dsp_ffi
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "cb7c6f259e9afb178052ec426872e75db5af46440ecdaec8e65c7c429e58b3be", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cb7c6f259e9afb178052ec426872e75db5af46440ecdaec8e65c7c429e58b3be", kill_on_drop: false }`
[INFO] [stdout] cb7c6f259e9afb178052ec426872e75db5af46440ecdaec8e65c7c429e58b3be
